﻿2026-09-09T05:21:52.3858574Z ##[group]Run .github/bench/wrap.ps1 -Step "twohost-web-a" -Command "cargo test -p spt-daemon --test twohost_web -- --nocapture"
2026-09-09T05:21:52.3859656Z [36;1m.github/bench/wrap.ps1 -Step "twohost-web-a" -Command "cargo test -p spt-daemon --test twohost_web -- --nocapture"[0m
2026-09-09T05:21:52.3865567Z shell: C:\Program Files\PowerShell\7\pwsh.EXE -command ". '{0}'"
2026-09-09T05:21:52.3866162Z env:
2026-09-09T05:21:52.3866627Z   SPT_CI_TEST_TMP: C:\actions-runner\_work\_temp\spt-test-tmp-34310511612-1-f2b74a14676e49f8bc3d6f31abeda698
2026-09-09T05:21:52.3867400Z   TEMP: C:\actions-runner\_work\_temp\spt-test-tmp-34310511612-1-f2b74a14676e49f8bc3d6f31abeda698
2026-09-09T05:21:52.3868031Z   TMP: C:\actions-runner\_work\_temp\spt-test-tmp-34310511612-1-f2b74a14676e49f8bc3d6f31abeda698
2026-09-09T05:21:52.3868452Z   SPT_TWO_HOST: 1
2026-09-09T05:21:52.3868657Z   SPT_TWO_HOST_ROLE: a
2026-09-09T05:21:52.3868860Z   SPT_TWO_HOST_SECRET: rig-twohost-ci
2026-09-09T05:21:52.3869112Z   SPT_TWO_HOST_PEER_IP: 100.98.197.12
2026-09-09T05:21:52.3869381Z   SPT_TWO_HOST_WAIT_SECS: 900
2026-09-09T05:21:52.3869586Z ##[endgroup]
2026-09-09T05:21:55.2241016Z    Compiling spt-daemon v0.68.0 (C:\actions-runner\_work\spt-bs-core\spt-bs-core\crates\spt-daemon)
2026-09-09T05:21:59.3430785Z     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.52s
2026-09-09T05:21:59.3768060Z      Running tests\twohost_web.rs (target\debug\deps\twohost_web-f73bc44be13353fb.exe)
2026-09-09T05:22:00.8148628Z 
2026-09-09T05:22:00.8149047Z running 5 tests
2026-09-09T05:22:00.8151195Z test two_host_web_role_b ... ok
2026-09-09T05:22:00.9325729Z TWOHOST-WEB role A cell 2: listener 51264, broker udp 7482 (spt-twohost-web-a2-15272), pid 15272
2026-09-09T05:22:00.9326491Z TWOHOST-WEB role A cell 0: listener 51263, broker udp 7480 (spt-twohost-web-a0-15272), pid 15272
2026-09-09T05:22:00.9336101Z TWOHOST-WEB role A cell 3: listener 51265, broker udp 7483 (spt-daemon-seed-2cb6f3b2e4cde772.sock), pid 15272
2026-09-09T05:22:00.9353386Z TWOHOST-WEB role A cell 1: listener 51271, broker udp 7481 (spt-twohost-web-a1-15272), pid 15272
2026-09-09T05:22:00.9454258Z TWOHOST-WEB role A helper: gateway row merged, verdicts [Merged(Inserted)]
2026-09-09T05:22:00.9460549Z CONN_LIFECYCLE: conn=4 role=brain wall_ms=1788931320945 mono_ms=0 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:00.9646427Z PAIR_MEET_UP:twohost step=59631044 id=63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11 addr=EndpointAddr { id: PublicKey(63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11), addrs: {Ip(100.68.35.65:63042), Ip(192.168.1.81:63042)} }
2026-09-09T05:22:00.9648538Z PAIR_MEET_UP:twohost step=59631044 id=63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11 addr=EndpointAddr { id: PublicKey(63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11), addrs: {Ip(100.68.35.65:63052), Ip(192.168.1.81:63052)} }
2026-09-09T05:22:00.9649753Z PAIR_MEET_UP:twohost step=59631044 id=63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11 addr=EndpointAddr { id: PublicKey(63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11), addrs: {Ip(100.68.35.65:63045), Ip(192.168.1.81:63045)} }
2026-09-09T05:22:00.9650844Z PAIR_MEET_UP:twohost step=59631044 id=63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11 addr=EndpointAddr { id: PublicKey(63ccc98cf91b0d65528b2743deda083e50edea2e8dbaddc4018e89889fe6ef11), addrs: {Ip(100.68.35.65:63044), Ip(192.168.1.81:63044)} }
2026-09-09T05:22:01.0044032Z CONN_LIFECYCLE: conn=1 role=brain wall_ms=1788931321004 mono_ms=58 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:01.0048506Z CONN_LIFECYCLE: conn=1 role=brain stream-subscriber stream=1 wall_ms=1788931321004 mono_ms=58 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:01.0050233Z CONN_LIFECYCLE: conn=3 role=brain wall_ms=1788931321004 mono_ms=58 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:01.0053267Z CONN_LIFECYCLE: conn=3 role=brain stream-subscriber stream=1 wall_ms=1788931321005 mono_ms=59 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:01.0068037Z CONN_LIFECYCLE: conn=2 role=brain wall_ms=1788931321006 mono_ms=60 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:01.0071132Z CONN_LIFECYCLE: conn=2 role=brain stream-subscriber stream=1 wall_ms=1788931321007 mono_ms=61 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:01.0422123Z TWOHOST OK: fetch of B's open.md through A is byte-equal
2026-09-09T05:22:01.0422438Z TWOHOST OK: Range through A is B's 206 with Content-Range
2026-09-09T05:22:01.0422693Z TWOHOST OK: B's WEB deny rule answers 403 naming WEB through A
2026-09-09T05:22:01.0441173Z test two_host_web_deny_role_a ... ok
2026-09-09T05:22:01.0441431Z test two_host_web_fetch_role_a ... ok
2026-09-09T05:22:01.0442309Z test two_host_web_range_role_a ... ok
2026-09-09T05:22:06.1954702Z CONN_LIFECYCLE: conn=5 role=brain wall_ms=1788931326195 mono_ms=5249 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.1958257Z CONN_LIFECYCLE: conn=5 role=brain wall_ms=1788931326195 mono_ms=5249 event=transport-close poisoned=false timed_out=false [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.1960297Z CONN_LIFECYCLE: conn=6 role=brain stream-subscriber stream=1 wall_ms=1788931326195 mono_ms=5249 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.1962730Z CONN_LIFECYCLE: conn=6 role=brain stream-subscriber stream=1 wall_ms=1788931326196 mono_ms=5250 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.1984166Z ACCESS_STORE_MINTED C:\actions-runner\_work\_temp\spt-test-tmp-34310511612-1-f2b74a14676e49f8bc3d6f31abeda698\.tmpOfjdJv\identity\trust\access.json — no access store was present at first load in this process, so an EMPTY baseline was written (everything open that the chain leaves open). If this node had access rules, they are GONE: the store was removed while the daemon was down, and this mint replaced it. Re-apply them (`spt endpoint access ...`); a restart cannot tell a wipe from a first boot.
2026-09-09T05:22:06.3397543Z CONN_LIFECYCLE: conn=6 role=brain stream-subscriber stream=1 wall_ms=1788931326339 mono_ms=5393 event=transport-close poisoned=false timed_out=false [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.3398441Z CONN_LIFECYCLE: conn=8 role=brain wall_ms=1788931326339 mono_ms=5393 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.3399442Z CONN_LIFECYCLE: conn=8 role=brain wall_ms=1788931326339 mono_ms=5393 event=transport-close poisoned=false timed_out=false [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.3558380Z CONN_LIFECYCLE: conn=7 role=brain wall_ms=1788931326355 mono_ms=5409 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.3561388Z CONN_LIFECYCLE: conn=7 role=brain stream-subscriber stream=2 wall_ms=1788931326356 mono_ms=5410 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.9473468Z TWOHOST OK: A's helperline gained quoted-by-the-user.md for msg BCDFGH23 in 6001 ms
2026-09-09T05:22:06.9566661Z CONN_LIFECYCLE: conn=9 role=brain wall_ms=1788931326956 mono_ms=6010 event=write-start [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.9570083Z CONN_LIFECYCLE: conn=9 role=brain stream-subscriber stream=3 wall_ms=1788931326956 mono_ms=6010 event=stream-sub-attach stream=3 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION]
2026-09-09T05:22:06.9791000Z F1_ARM=vii: EXECUTED, the audience's node pulled the quoted file byte-equal
2026-09-09T05:22:06.9791449Z TWOHOST OK: the audience's node fetched the user's quoted file byte-equal
2026-09-09T05:22:06.9825269Z test two_host_web_helper_role_a ... ok
2026-09-09T05:22:06.9825472Z 
2026-09-09T05:22:06.9825716Z test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 6.17s
2026-09-09T05:22:06.9826774Z 
